**** dT 0.000 * top TEST ../../../../bin/vinyltest/tests/c00113.vtc starting **** top extmacro def pkg_version=trunk **** top extmacro def pkg_branch=trunk **** top extmacro def pwd=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest **** top extmacro def date(...) **** top extmacro def string(...) **** top extmacro def localhost=127.0.0.1 **** top extmacro def bad_backend=127.0.0.1:60094 **** top extmacro def listen_addr=127.0.0.1:0 **** top extmacro def bad_ip=192.0.2.255 **** top extmacro def topbuild=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub **** top extmacro def topsrc=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/../.. **** top macro def testdir=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/../../../../bin/vinyltest/tests **** top macro def tmpdir=/tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184 **** top macro def vtcid=vtc.960727.50bb3184 **** dT 0.001 ** top === vtest "probe expect close" * top VTEST probe expect close ** top === server s0 { **** s0 macro def s0_addr=127.0.0.1 **** s0 macro def s0_port=50069 **** s0 macro def s0_sock=127.0.0.1:50069 ** s0 Starting dispatch server ** top === vinyl v1 -vcl+backend { **** dT 0.002 ** s0 Dispatch started on 127.0.0.1:50069 **** dT 0.012 ** v1 Launch *** v1 CMD: cd ${pwd} && exec vinyld -d -n /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 35772' -P /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v1/vinyld.pid -p vmod_path=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: *** v1 CMD: cd /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld -d -n /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v1 -i v1 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 35772' -P /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v1/vinyld.pid -p vmod_path=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: **** dT 0.015 *** v1 PID: 960777 **** v1 macro def v1_pid=960777 **** v1 macro def v1_name=/tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v1 **** dT 0.058 *** v1 debug|Warning: mlock() of VSM failed: Not owner (1) **** dT 0.061 *** v1 debug|Debug: Version: vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v1 debug|Debug: Platform: -jsolaris,-sdefault,-sdefault,-hcritbit *** v1 debug|200 292 *** v1 debug|----------------------------- *** v1 debug|Vinyl Cache CLI 1.0 *** v1 debug|----------------------------- *** v1 debug|-jsolaris,-sdefault,-sdefault,-hcritbit *** v1 debug|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v1 debug| *** v1 debug|Type 'help' for command list. *** v1 debug|Type 'quit' to close CLI session. *** v1 debug|Type 'start' to launch worker process. *** v1 debug| **** dT 0.158 **** v1 CLIPOLL 1 0x1 0x0 0x0 *** v1 CLI connection fd = 6 *** v1 CLI RX 107 **** v1 CLI RX|atupnapqauoejofubqjzisdatdrtibvc **** v1 CLI RX| **** v1 CLI RX|Authentication required. **** dT 0.159 **** v1 CLI TX|auth 9016a19ff66ff30cce21a1c89df1b126fd66277c0c6ce5fb3a8d073d6330be8b *** v1 CLI RX 200 **** v1 CLI RX|----------------------------- **** v1 CLI RX|Vinyl Cache CLI 1.0 **** v1 CLI RX|----------------------------- **** v1 CLI RX|-jsolaris,-sdefault,-sdefault,-hcritbit **** v1 CLI RX|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 **** v1 CLI RX| **** v1 CLI RX|Type 'help' for command list. **** v1 CLI RX|Type 'quit' to close CLI session. **** v1 CLI RX|Type 'start' to launch worker process. **** dT 0.160 **** v1 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P **** v1 CLI TX|vcl 4.1; **** v1 CLI TX|backend s0 { .host = "127.0.0.1"; .port = "50069"; } **** v1 CLI TX| **** v1 CLI TX| **** v1 CLI TX|\tprobe default { **** v1 CLI TX|\t\t.window = 3; **** v1 CLI TX|\t\t.threshold = 1; **** v1 CLI TX|\t\t.timeout = 0.5s; **** v1 CLI TX|\t\t.interval = 0.1s; **** v1 CLI TX|\t\t.expect_close = true; **** v1 CLI TX|\t} **** v1 CLI TX| **** v1 CLI TX|%XJEIFLH|)Xspa8P **** dT 0.260 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.360 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.460 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.560 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.660 *** v1 vsl|No VSL chunk found (child not started ?) **** dT 0.727 *** v1 CLI RX 200 **** v1 CLI RX|Message from VCC-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|Message from C-compiler: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|cc: Warning: Option -fno-var-tracking-assignments passed to ld, if ld is invoked, ignored otherwise **** v1 CLI RX|"vgc.c", line 3190: warning: statement not reached (E_STATEMENT_NOT_REACHED) **** v1 CLI RX|Message from dlopen: **** v1 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v1 CLI RX|VCL compiled. **** v1 CLI TX|vcl.use vcl1 *** v1 CLI RX 200 **** v1 CLI RX|VCL 'vcl1' now active ** v1 Start **** v1 CLI TX|start **** dT 0.740 *** v1 debug|Debug: *** v1 debug|Child (961006) Started **** dT 0.770 *** v1 debug|Child launched OK **** dT 0.773 *** s0 dispatch fd 4 -> s1 *** s1 start with fd 4 *** v1 debug|Info: Child (961006) said Child starts *** v1 CLI RX 200 *** v1 debug| *** v1 debug|Info: *** v1 wait-running *** v1 debug| Child (961006) said notice:\tlibumem was already found to be loaded *** v1 debug|Info: **** v1 CLI TX|status *** v1 debug|Child (961006) said Security: proc_setid missing, uid/gid unchanged ** s1 === rxreq *** v1 CLI RX 200 **** v1 CLI RX|Child in state running **** v1 CLI TX|debug.listen_address **** s1 rxhdr|GET / HTTP/1.1\r **** s1 rxhdr|Host: 127.0.0.1\r **** s1 rxhdr|Connection: close\r **** s1 rxhdr|\r **** s1 rxhdrlen = 54 **** s1 http[ 0] |GET *** v1 CLI RX 200 **** s1 http[ 1] |/ **** s1 http[ 2] |HTTP/1.1 **** s1 http[ 3] |Host: 127.0.0.1 **** s1 http[ 4] |Connection: close **** v1 CLI RX|a0 127.0.0.1 61782 **** v1 CLI TX|debug.xid 1000 **** s1 bodylen = 0 ** s1 === txresp **** s1 txresp|HTTP/1.1 200 OK\r **** s1 txresp|Date: Tue, 17 Mar 2026 08:19:02 GMT\r **** s1 txresp|Server: s1\r **** s1 txresp|Content-Length: 0\r **** s1 txresp|\r ** s1 === expect_close **** s1 Expecting close (fd = 4) *** v1 CLI RX 200 **** v1 CLI RX|XID is 1000 chunk 1 **** v1 CLI TX|debug.listen_address *** v1 CLI RX 200 **** v1 CLI RX|a0 127.0.0.1 61782 ** v1 Listen on 127.0.0.1 61782 **** v1 macro def v1_addr=127.0.0.1 **** v1 macro def v1_port=61782 **** v1 macro def v1_sock=127.0.0.1:61782 **** v1 macro def v1_a0_addr=127.0.0.1 **** v1 macro def v1_a0_port=61782 **** v1 macro def v1_a0_sock=127.0.0.1:61782 **** dT 0.861 **** v1 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1773735541.863326/vgc.so 1auto **** v1 vsl| 0 Backend_health - s0 Went sick -------- 0 1 3 0.000000 0.000000 "" **** v1 vsl| 0 Backend_health - s0 Still sick -------- 0 1 3 0.000000 0.000000 "" **** v1 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1773735541.863326/vgc.so" as "vcl1" **** v1 vsl| 0 CLI - Rd vcl.use "vcl1" **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd start **** v1 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:61782 **** v1 vsl| 0 Debug - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:61782 **** v1 vsl| 0 CLI - Wr 200 0 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 61782 **** v1 vsl| 0 CLI - Rd debug.xid 1000 **** v1 vsl| 0 CLI - Wr 200 19 XID is 1000 chunk 1 **** v1 vsl| 0 CLI - Rd debug.listen_address **** v1 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 61782 **** dT 0.873 ** top === vinyl v2 -vcl+backend { **** dT 0.884 ** v2 Launch *** v2 CMD: cd ${pwd} && exec vinyld -d -n /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v2 -i v2 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 58668' -P /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v2/vinyld.pid -p vmod_path=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: *** v2 CMD: cd /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest && exec vinyld -d -n /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v2 -i v2 -l 2m -p auto_restart=off -p syslog_cli_traffic=off -p thread_pool_min=10 -p debug=+vtc_mode -p vsl_mask=+Debug,+H2RxHdr,+H2RxBody -p h2_initial_window_size=1m -p h2_rx_window_low_water=64k -a '127.0.0.1:0' -M '127.0.0.1 58668' -P /tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v2/vinyld.pid -p vmod_path=/tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/vmod/.libs: **** dT 0.888 *** v2 PID: 961020 **** v2 macro def v2_pid=961020 **** v2 macro def v2_name=/tmp/vtest.suncc12.6_m64_IPv4_uffix/_vtest_tmp/vtc.960727.50bb3184/v2 **** dT 0.927 *** v2 debug|Warning: mlock() of VSM failed: Not owner (1 *** v2 debug|) **** dT 0.930 *** v2 debug|Debug: Version: vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v2 debug|Debug: Platform: -jsolaris,-sdefault,-sdefault,-hcritbit *** v2 debug|200 292 *** v2 debug|----------------------------- *** v2 debug|Vinyl Cache CLI 1.0 *** v2 debug|----------------------------- *** v2 debug|-jsolaris,-sdefault,-sdefault,-hcritbit *** v2 debug|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 *** v2 debug| *** v2 debug|Type 'help' for command list. *** v2 debug|Type 'quit' to close CLI session. *** v2 debug|Type 'start' to launch worker process. *** v2 debug| **** dT 1.027 **** v2 CLIPOLL 1 0x1 0x0 0x0 *** v2 CLI connection fd = 18 **** dT 1.028 *** v2 CLI RX 107 **** v2 CLI RX|szmsdfuszybjtnvjapwafyokwdqlfafz **** v2 CLI RX| **** v2 CLI RX|Authentication required. **** v2 CLI TX|auth 39a24fb6e84da57c5acfa931ab89bbf06f10defd788b63d0ebb2e83372172d15 **** dT 1.029 *** v2 CLI RX 200 **** v2 CLI RX|----------------------------- **** v2 CLI RX|Vinyl Cache CLI 1.0 **** v2 CLI RX|----------------------------- **** v2 CLI RX|-jsolaris,-sdefault,-sdefault,-hcritbit **** v2 CLI RX|vinyl-cache-trunk revision 17ea9216e8091e8bd4b65a2e0b946c92de2125f4 **** v2 CLI RX| **** v2 CLI RX|Type 'help' for command list. **** v2 CLI RX|Type 'quit' to close CLI session. **** v2 CLI RX|Type 'start' to launch worker process. **** v2 CLI TX|vcl.inline vcl1 << %XJEIFLH|)Xspa8P **** v2 CLI TX|vcl 4.1; **** v2 CLI TX|backend s0 { .host = "127.0.0.1"; .port = "50069"; } **** v2 CLI TX| **** v2 CLI TX| **** v2 CLI TX|\tprobe default { **** v2 CLI TX|\t\t.window = 3; **** v2 CLI TX|\t\t.threshold = 1; **** v2 CLI TX|\t\t.timeout = 0.5s; **** v2 CLI TX|\t\t.interval = 0.1s; **** v2 CLI TX|\t\t.expect_close = false; **** v2 CLI TX|\t} **** v2 CLI TX| **** v2 CLI TX|%XJEIFLH|)Xspa8P **** dT 1.129 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 1.229 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 1.272 **** s1 fd=4 EOF, as expected *** s1 shutting fd 4 (server dispatch) ** s1 Ending **** dT 1.329 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 1.361 **** v1 vsl| 0 Backend_health - s0 Still sick 4---Xr-- 0 1 3 0.000000 0.000000 "Poll error 145 (Connection timed out)" **** dT 1.372 *** s0 dispatch fd 16 -> s2 **** dT 1.373 *** s2 start with fd 16 ** s2 === rxreq **** s2 rxhdr|GET / HTTP/1.1\r **** s2 rxhdr|Host: 127.0.0.1\r **** s2 rxhdr|Connection: close\r **** s2 rxhdr|\r **** s2 rxhdrlen = 54 **** s2 http[ 0] |GET **** s2 http[ 1] |/ **** s2 http[ 2] |HTTP/1.1 **** s2 http[ 3] |Host: 127.0.0.1 **** s2 http[ 4] |Connection: close **** s2 bodylen = 0 ** s2 === txresp **** s2 txresp|HTTP/1.1 200 OK\r **** s2 txresp|Date: Tue, 17 Mar 2026 08:19:03 GMT\r **** s2 txresp|Server: s2\r **** s2 txresp|Content-Length: 0\r **** s2 txresp|\r ** s2 === expect_close **** s2 Expecting close (fd = 16) **** dT 1.429 *** v2 vsl|No VSL chunk found (child not started ?) **** dT 1.498 *** v2 CLI RX 200 **** v2 CLI RX|Message from VCC-compiler: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|Message from C-compiler: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|cc: Warning: Option -fno-var-tracking-assignments passed to ld, if ld is invoked, ignored otherwise **** v2 CLI RX|"vgc.c", line 3190: warning: statement not reached (E_STATEMENT_NOT_REACHED) **** v2 CLI RX|Message from dlopen: **** v2 CLI RX|Security: proc_setid missing, uid/gid unchanged **** v2 CLI RX|VCL compiled. **** v2 CLI TX|vcl.use vcl1 **** dT 1.499 *** v2 CLI RX 200 **** v2 CLI RX|VCL 'vcl1' now active ** v2 Start **** v2 CLI TX|start **** dT 1.512 *** v2 debug|Debug: Child (961129) Started *** v2 debug| **** dT 1.541 *** v2 debug|Child launched OK **** dT 1.543 *** s0 dispatch fd 4 -> s3 *** v2 CLI RX 200 *** v2 wait-running **** v2 CLI TX|status *** v2 debug|Info: Child (961129) said Child starts *** v2 debug| *** v2 debug|Info: Child (961129) said notice:\tlibumem was already found to be loaded *** v2 debug| *** v2 debug|Info: *** v2 debug| *** v2 debug|Child (961129) said Security: proc_setid missing, uid/gid unchanged *** v2 debug| *** v2 CLI RX 200 **** v2 CLI RX|Child in state running **** v2 CLI TX|debug.listen_address **** dT 1.544 *** v2 CLI RX 200 **** v2 CLI RX|a0 127.0.0.1 54393 **** v2 CLI TX|debug.xid 1000 *** v2 CLI RX 200 **** v2 CLI RX|XID is 1000 chunk 1 **** v2 CLI TX|debug.listen_address *** v2 CLI RX 200 **** v2 CLI RX|a0 127.0.0.1 54393 ** v2 Listen on 127.0.0.1 54393 **** v2 macro def v2_addr=127.0.0.1 **** v2 macro def v2_port=54393 **** v2 macro def v2_sock=127.0.0.1:54393 **** v2 macro def v2_a0_addr=127.0.0.1 ---- s3 Assert error in server_dispatch_thread(), ../../../../bin/vinyltest/vtest2/src/vtc_server.c line 368: Condition(pthread_create(&s2->tp, ((void *)0), server_dispatch_wrk, s2) failed) not true. Errno=11 Resource temporarily unavailable Backtrace: fffffc5e4bde2b7d: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'vbt_execinfo+0x3d [0xfffffc5e4bde2b7d] fffffc5e4bde2f21: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'VBT_format+0x41 [0xfffffc5e4bde2f21] fffffc5e4bde2fd0: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'VBT_dump+0x90 [0xfffffc5e4bde2fd0] 47162d: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'vtc_log_VAS_Fail+0xcd [0x47162d] fffffc5e4bde14ac: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'VAS_Fail+0x8c [0xfffffc5e4bde14ac] 48d1d5: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'server_dispatch_thread+0x535 [0x48d1d5] fffffc7fef2356e7: /lib/amd64/libc.so.1'_thrp_setup+0x77 [0xfffffc7fef2356e7] fffffc7fef235a30: /lib/amd64/libc.so.1'_lwp_start+0x0 [0xfffffc7fef235a30] **** v2 macro def v2_a0_port=54393 **** v2 macro def v2_a0_sock=127.0.0.1:54393 **** dT 1.630 **** v2 vsl| 0 CLI - Rd vcl.load "vcl1" vcl_vcl1.1773735542.732590/vgc.so 1auto **** v2 vsl| 0 Backend_health - s0 Went sick -------- 0 1 3 0.000000 0.000000 "" **** v2 vsl| 0 Backend_health - s0 Still sick -------- 0 1 3 0.000000 0.000000 "" **** v2 vsl| 0 CLI - Wr 200 52 Loaded "vcl_vcl1.1773735542.732590/vgc.so" as "vcl1" **** v2 vsl| 0 CLI - Rd vcl.use "vcl1" **** v2 vsl| 0 CLI - Wr 200 0 **** v2 vsl| 0 CLI - Rd start **** v2 vsl| 0 Debug - sockopt: Setting SO_LINGER for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting SO_KEEPALIVE for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting SO_SNDTIMEO for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting SO_RCVTIMEO for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting TCP_NODELAY for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting TCP_KEEPIDLE for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting TCP_KEEPCNT for a0=127.0.0.1:54393 **** v2 vsl| 0 Debug - sockopt: Setting TCP_KEEPINTVL for a0=127.0.0.1:54393 **** v2 vsl| 0 CLI - Wr 200 0 **** v2 vsl| 0 CLI - Rd debug.listen_address **** v2 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 54393 **** v2 vsl| 0 CLI - Rd debug.xid 1000 **** v2 vsl| 0 CLI - Wr 200 19 XID is 1000 chunk 1 **** v2 vsl| 0 CLI - Rd debug.listen_address **** v2 vsl| 0 CLI - Wr 200 19 a0 127.0.0.1 54393 **** dT 1.644 * top Aborting execution, test failed * top RESETTING after ../../../../bin/vinyltest/tests/c00113.vtc ** s0 Waiting for server (3/-1) ** s1 Waiting for server (-1/-1) ** s2 Waiting for server (-1/16) ** s3 Waiting for server (-1/4) **** dT 1.645 ---- v2 Assert error in server_wait(), ../../../../bin/vinyltest/vtest2/src/vtc_server.c line 414: Condition(pthread_join(s->tp, &res) failed) not true. Errno=3 No such process Backtrace: fffffc5e4bde2b7d: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'vbt_execinfo+0x3d [0xfffffc5e4bde2b7d] fffffc5e4bde2f21: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'VBT_format+0x41 [0xfffffc5e4bde2f21] fffffc5e4bde2fd0: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'VBT_dump+0x90 [0xfffffc5e4bde2fd0] 47162d: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'vtc_log_VAS_Fail+0xcd [0x47162d] fffffc5e4bde14ac: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/lib/libvinylapi/.libs/libvinylapi.so.3.1.0'VAS_Fail+0x8c [0xfffffc5e4bde14ac] 48d761: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'server_wait+0x181 [0x48d761] 48e05d: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'cmd_server+0x27d [0x48e05d] 437d52: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'reset_cmd+0x92 [0x437d52] 437dcb: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'reset_cmds+0x2b [0x437dcb] 438112: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'fail_out+0xf2 [0x438112] 438924: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'exec_file+0x704 [0x438924] 47d9e2: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'start_test+0x982 [0x47d9e2] 480edb: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'main+0x53b [0x480edb] 428534: /tmp/vtest.suncc12.6_m64_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/.libs/vinyltest'0x28534 [0x428534] * top failure during reset # top TEST ../../../../bin/vinyltest/tests/c00113.vtc FAILED (1.651) exit=2 FAIL tests/c00113.vtc (exit status: 2)